[INFO] fetching crate stagecrew 0.4.3...
[INFO] testing stagecrew-0.4.3 against try#b8e88e5ddf5521a9f43ee3f62a702388c713e4bb for pr-155114
[INFO] extracting crate stagecrew 0.4.3 into /workspace/builds/worker-1-tc2/source
[INFO] removed /workspace/builds/worker-1-tc2/source/rust-toolchain.toml
[INFO] started tweaking crates.io crate stagecrew 0.4.3
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate stagecrew 0.4.3
[INFO] tweaked toml for crates.io crate stagecrew 0.4.3 written to /workspace/builds/worker-1-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate stagecrew 0.4.3 on toolchain b8e88e5ddf5521a9f43ee3f62a702388c713e4bb
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+b8e88e5ddf5521a9f43ee3f62a702388c713e4bb" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate stagecrew 0.4.3 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+b8e88e5ddf5521a9f43ee3f62a702388c713e4bb" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+b8e88e5ddf5521a9f43ee3f62a702388c713e4bb" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] da405cfb783bfe819df497e566509c90ec2a4e52c2e8176f4c77eaa21811edc8
[INFO] running `Command { std: "docker" "start" "-a" "da405cfb783bfe819df497e566509c90ec2a4e52c2e8176f4c77eaa21811edc8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "da405cfb783bfe819df497e566509c90ec2a4e52c2e8176f4c77eaa21811edc8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "da405cfb783bfe819df497e566509c90ec2a4e52c2e8176f4c77eaa21811edc8", kill_on_drop: false }`
[INFO] [stdout] da405cfb783bfe819df497e566509c90ec2a4e52c2e8176f4c77eaa21811edc8
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+b8e88e5ddf5521a9f43ee3f62a702388c713e4bb" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 8c46ad56158efd42f968653faac1ab33687ca05fa711b2d57c0b3e3366dbd104
[INFO] running `Command { std: "docker" "start" "-a" "8c46ad56158efd42f968653faac1ab33687ca05fa711b2d57c0b3e3366dbd104", kill_on_drop: false }`
[INFO] [stderr]    Compiling lock_api v0.4.14
[INFO] [stderr]    Compiling syn v2.0.114
[INFO] [stderr]    Compiling mio v1.1.1
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling zmij v1.0.19
[INFO] [stderr]    Compiling signal-hook v0.3.18
[INFO] [stderr]    Compiling mockall_derive v0.13.1
[INFO] [stderr]    Compiling num-conv v0.2.0
[INFO] [stderr]    Compiling rustix v1.1.3
[INFO] [stderr]    Compiling ryu v1.0.22
[INFO] [stderr]    Compiling predicates-core v1.0.10
[INFO] [stderr]    Compiling libsqlite3-sys v0.36.0
[INFO] [stderr]    Compiling foldhash v0.2.0
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling termtree v0.5.1
[INFO] [stderr]    Compiling dirs-sys v0.5.0
[INFO] [stderr]    Compiling time-macros v0.2.27
[INFO] [stderr]    Compiling predicates-tree v1.0.13
[INFO] [stderr]    Compiling compact_str v0.8.1
[INFO] [stderr]    Compiling hashbrown v0.16.1
[INFO] [stderr]    Compiling predicates v3.1.4
[INFO] [stderr]    Compiling crossbeam-queue v0.3.12
[INFO] [stderr]    Compiling crossbeam-channel v0.5.15
[INFO] [stderr]    Compiling downcast v0.11.0
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling signal-hook-mio v0.2.5
[INFO] [stderr]    Compiling fragile v2.0.1
[INFO] [stderr]    Compiling winnow v0.7.14
[INFO] [stderr]    Compiling rustc-demangle v0.1.27
[INFO] [stderr]    Compiling chrono v0.4.43
[INFO] [stderr]    Compiling dirs v6.0.0
[INFO] [stderr]    Compiling crossterm v0.28.1
[INFO] [stderr]    Compiling hashlink v0.11.0
[INFO] [stderr]    Compiling serde_spanned v1.0.4
[INFO] [stderr]    Compiling backtrace v0.3.76
[INFO] [stderr]    Compiling toml_writer v1.0.6+spec-1.1.0
[INFO] [stderr]    Compiling fallible-streaming-iterator v0.1.9
[INFO] [stderr]    Compiling fallible-iterator v0.3.0
[INFO] [stderr]    Compiling csv v1.4.0
[INFO] [stderr]    Compiling shellexpand v3.1.1
[INFO] [stderr]    Compiling xdg v3.0.0
[INFO] [stderr]    Compiling jiff v0.2.18
[INFO] [stderr]    Compiling crossbeam v0.8.4
[INFO] [stderr]    Compiling jwalk v0.8.1
[INFO] [stderr]    Compiling time v0.3.47
[INFO] [stderr]    Compiling trash v5.2.5
[INFO] [stderr]    Compiling toml_parser v1.0.6+spec-1.1.0
[INFO] [stderr]    Compiling simplelog v0.12.2
[INFO] [stderr]    Compiling toml v0.9.11+spec-1.1.0
[INFO] [stderr]    Compiling darling_core v0.23.0
[INFO] [stderr]    Compiling serde_derive_internals v0.29.1
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling derive_more-impl v2.1.1
[INFO] [stderr]    Compiling strum_macros v0.26.4
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling futures-macro v0.3.31
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling ref-cast-impl v1.0.25
[INFO] [stderr]    Compiling clap_derive v4.5.55
[INFO] [stderr]    Compiling tokio-macros v2.6.0
[INFO] [stderr]    Compiling schemars_derive v1.2.1
[INFO] [stderr]    Compiling ref-cast v1.0.25
[INFO] [stderr]    Compiling tokio v1.49.0
[INFO] [stderr]    Compiling derive_more v2.1.1
[INFO] [stderr]    Compiling crossterm v0.29.0
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling tracing-subscriber v0.3.22
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling clap v4.5.56
[INFO] [stderr]    Compiling clap-verbosity-flag v3.0.4
[INFO] [stderr]    Compiling unicode-plot v0.1.0
[INFO] [stderr]    Compiling strum v0.26.3
[INFO] [stderr]    Compiling inquire v0.9.4
[INFO] [stderr]    Compiling darling_macro v0.23.0
[INFO] [stderr]    Compiling darling v0.23.0
[INFO] [stderr]    Compiling instability v0.3.11
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling ratatui v0.29.0
[INFO] [stderr]    Compiling mockall v0.13.1
[INFO] [stderr]    Compiling tracing-error v0.2.1
[INFO] [stderr]    Compiling termbg v0.6.2
[INFO] [stderr]    Compiling schemars v1.2.1
[INFO] [stderr]    Compiling color-spantrace v0.3.0
[INFO] [stderr]    Compiling color-eyre v0.6.5
[INFO] [stderr]    Compiling futures-executor v0.3.31
[INFO] [stderr]    Compiling futures v0.3.31
[INFO] [stderr]    Compiling tui-piechart v0.2.8
[INFO] [stderr]    Compiling rusqlite v0.38.0
[INFO] [stderr]    Compiling stagecrew v0.4.3 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 51.31s
[INFO] running `Command { std: "docker" "inspect" "8c46ad56158efd42f968653faac1ab33687ca05fa711b2d57c0b3e3366dbd104", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8c46ad56158efd42f968653faac1ab33687ca05fa711b2d57c0b3e3366dbd104", kill_on_drop: false }`
[INFO] [stdout] 8c46ad56158efd42f968653faac1ab33687ca05fa711b2d57c0b3e3366dbd104
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+b8e88e5ddf5521a9f43ee3f62a702388c713e4bb" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 15b004f007bda428e845b4dad15503fa3eddb103c41ecd0c93b837df7b282958
[INFO] running `Command { std: "docker" "start" "-a" "15b004f007bda428e845b4dad15503fa3eddb103c41ecd0c93b837df7b282958", kill_on_drop: false }`
[INFO] [stderr]    Compiling rustix v1.1.3
[INFO] [stderr]    Compiling regex-automata v0.4.13
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling zerocopy v0.8.37
[INFO] [stderr]    Compiling wait-timeout v0.2.1
[INFO] [stderr]    Compiling bit-vec v0.8.0
[INFO] [stderr]    Compiling tracing-test-macro v0.2.6
[INFO] [stderr]    Compiling unarray v0.1.4
[INFO] [stderr]    Compiling filetime v0.2.27
[INFO] [stderr]    Compiling rand_core v0.9.5
[INFO] [stderr]    Compiling bit-set v0.8.0
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]    Compiling rand_xorshift v0.4.0
[INFO] [stderr]    Compiling chrono v0.4.43
[INFO] [stderr]    Compiling trash v5.2.5
[INFO] [stderr]    Compiling matchers v0.2.0
[INFO] [stderr]    Compiling tracing-subscriber v0.3.22
[INFO] [stderr]    Compiling crossterm v0.29.0
[INFO] [stderr]    Compiling tempfile v3.24.0
[INFO] [stderr]    Compiling rusty-fork v0.3.1
[INFO] [stderr]    Compiling inquire v0.9.4
[INFO] [stderr]    Compiling tracing-error v0.2.1
[INFO] [stderr]    Compiling tracing-test v0.2.6
[INFO] [stderr]    Compiling color-spantrace v0.3.0
[INFO] [stderr]    Compiling color-eyre v0.6.5
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling stagecrew v0.4.3 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling proptest v1.9.0
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 39.17s
[INFO] running `Command { std: "docker" "inspect" "15b004f007bda428e845b4dad15503fa3eddb103c41ecd0c93b837df7b282958", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "15b004f007bda428e845b4dad15503fa3eddb103c41ecd0c93b837df7b282958", kill_on_drop: false }`
[INFO] [stdout] 15b004f007bda428e845b4dad15503fa3eddb103c41ecd0c93b837df7b282958
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+b8e88e5ddf5521a9f43ee3f62a702388c713e4bb" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] cc1747b37750fe4f253007c41649bde91668f6eb078a13a174584af77706ecbe
[INFO] running `Command { std: "docker" "start" "-a" "cc1747b37750fe4f253007c41649bde91668f6eb078a13a174584af77706ecbe", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.39s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/stagecrew-0d3b507f3d71cbe5)
[INFO] [stdout] 
[INFO] [stdout] running 175 tests
[INFO] [stdout] test audit::tests::audit_action_as_str_matches_schema_check_constraint ... ok
[INFO] [stdout] test audit::tests::audit_service_current_user_reads_environment ... ok
[INFO] [stdout] test audit::tests::export_format_next_cycles_correctly ... ok
[INFO] [stdout] test audit::tests::export_empty_audit_log_produces_valid_output ... ok
[INFO] [stdout] test audit::tests::export_csv_produces_valid_csv_with_header ... ok
[INFO] [stdout] test audit::tests::audit_service_list_by_path_returns_empty_for_nonexistent ... ok
[INFO] [stdout] test audit::tests::export_csv_handles_special_characters_in_fields ... ok
[INFO] [stdout] test audit::tests::audit_service_list_recent_with_zero_limit ... ok
[INFO] [stdout] test config::tests::app_config_for_root_returns_global_when_no_local ... ok
[INFO] [stdout] test config::tests::app_config_from_global_has_empty_per_root ... ok
[INFO] [stdout] test audit::tests::export_jsonl_preserves_null_optional_fields ... ok
[INFO] [stdout] test audit::tests::audit_service_records_entry ... ok
[INFO] [stdout] test audit::tests::audit_service_list_recent_on_empty_db ... ok
[INFO] [stdout] test config::tests::app_config_handles_malformed_local_config ... ok
[INFO] [stdout] test config::tests::config_default_values ... ok
[INFO] [stdout] test audit::tests::audit_service_records_all_fields ... ok
[INFO] [stdout] test config::tests::config_deserializes_from_toml ... ok
[INFO] [stdout] test audit::tests::audit_service_records_entry_without_target_path ... ok
[INFO] [stdout] test config::tests::app_config_load_per_root_clears_previous ... ok
[INFO] [stdout] test config::tests::app_config_load_per_root_discovers_local_configs ... ok
[INFO] [stdout] test audit::tests::audit_service_list_by_path_filters_correctly ... ok
[INFO] [stdout] test config::tests::config_expands_tilde_only_prefix ... ok
[INFO] [stdout] test config::tests::config_expands_tilde_in_database_path ... ok
[INFO] [stdout] test config::tests::config_load_expands_tilde_in_tracked_paths ... ok
[INFO] [stdout] test config::tests::config_serializes_to_toml ... ok
[INFO] [stdout] test config::tests::config_schema_includes_scan_start_time ... ok
[INFO] [stdout] test config::tests::config_uses_defaults_for_missing_fields ... ok
[INFO] [stdout] test config::tests::config_rejects_invalid_scan_start_time ... ok
[INFO] [stdout] test config::tests::config_handles_paths_without_tilde ... ok
[INFO] [stdout] test config::tests::config_file_uses_override_path ... ok
[INFO] [stdout] test config::tests::app_config_reload_refreshes_configs ... ok
[INFO] [stdout] test config::tests::config_file_falls_back_to_xdg_when_no_override ... ok
[INFO] [stdout] test config::tests::database_file_derives_from_tracked_paths ... ok
[INFO] [stdout] test config::tests::database_file_falls_back_to_xdg_when_no_tracked_paths ... ok
[INFO] [stdout] test config::tests::local_config_merge_overrides_base_values ... ok
[INFO] [stdout] test config::tests::database_file_falls_back_to_config_when_no_override ... ok
[INFO] [stdout] test config::tests::local_config_merge_overrides_non_expiration_fields ... ok
[INFO] [stdout] test config::tests::local_config_merge_preserves_base_when_none ... ok
[INFO] [stdout] test config::tests::database_file_uses_override_path ... ok
[INFO] [stdout] test config::tests::database_file_explicit_path_takes_precedence_over_tracked_paths ... ok
[INFO] [stdout] test audit::tests::record_event_blocked_outcome_emits_warn_level ... ok
[INFO] [stdout] test config::tests::local_config_loads_from_root_directory ... ok
[INFO] [stdout] test config::tests::local_config_rejects_tracked_paths ... ok
[INFO] [stdout] test config::tests::local_config_nonexistent_root_returns_none ... ok
[INFO] [stdout] test config::tests::local_config_returns_none_when_missing ... ok
[INFO] [stdout] test audit::tests::export_jsonl_produces_valid_json_lines ... ok
[INFO] [stdout] test config::tests::database_file_override_beats_config_database_path ... ok
[INFO] [stdout] test config::tests::local_config_rejects_database_path ... ok
[INFO] [stdout] test config::tests::local_config_path_is_directory_returns_error ... ok
[INFO] [stdout] test config::tests::database_file_uses_explicit_path_when_set ... ok
[INFO] [stdout] test config::tests::local_config_rejects_wrong_field_types ... ok
[INFO] [stdout] test audit::tests::audit_service_records_all_action_types ... ok
[INFO] [stdout] test config::tests::local_config_rejects_unknown_fields ... ok
[INFO] [stdout] test audit::tests::audit_service_list_recent_orders_by_timestamp_desc ... ok
[INFO] [stdout] test db::tests::database_open_fails_on_invalid_path ... ok
[INFO] [stdout] test audit::tests::audit_service_list_recent_respects_limit ... ok
[INFO] [stdout] test audit::tests::record_event_blocked_outcome_writes_db_row ... ok
[INFO] [stdout] test audit::tests::record_event_writes_db_row_and_emits_tracing_event ... ok
[INFO] [stdout] test audit::tests::record_event_scanner_transition_emits_tracing_event ... ok
[INFO] [stdout] test config::tests::local_config_unreadable_file_returns_error ... FAILED
[INFO] [stdout] test db::tests::database_open_rejects_future_schema_version ... ok
[INFO] [stdout] test audit::tests::record_event_scanner_transition_writes_db_row ... ok
[INFO] [stdout] test db::tests::database_creates_indexes ... ok
[INFO] [stdout] test db::tests::database_initializes_stats_singleton ... ok
[INFO] [stdout] test db::tests::database_enables_wal_mode ... ok
[INFO] [stdout] test db::tests::database_creates_file_and_schema ... ok
[INFO] [stdout] test db::tests::compute_live_stats_counts_entries ... ok
[INFO] [stdout] test db::tests::compute_live_stats_prefers_active_rows_over_ignored_overlap_rows ... ok
[INFO] [stdout] test db::tests::compute_live_stats_cross_connection_visibility ... ok
[INFO] [stdout] test db::tests::compute_live_stats_deduplicates_overlapping_paths ... ok
[INFO] [stdout] test db::tests::database_enables_foreign_keys ... ok
[INFO] [stdout] test db::tests::database_open_upgrades_legacy_unversioned_schema ... ok
[INFO] [stdout] test db::tests::database_schema_is_idempotent ... ok
[INFO] [stdout] test db::tests::database_sets_schema_user_version ... ok
[INFO] [stdout] test db::tests::delete_root_fails_on_nonexistent ... ok
[INFO] [stdout] test db::tests::defer_entry_fails_on_nonexistent ... ok
[INFO] [stdout] test db::tests::entries_rejects_invalid_status ... ok
[INFO] [stdout] test db::tests::delete_root_removes_root ... ok
[INFO] [stdout] test db::tests::defer_entry_sets_status_and_timestamp ... ok
[INFO] [stdout] test db::tests::foreign_key_constraint_prevents_orphan_entries ... ok
[INFO] [stdout] test db::tests::get_entry_by_path_returns_none_when_not_found ... ok
[INFO] [stdout] test db::tests::delete_root_cascades_to_entries ... ok
[INFO] [stdout] test db::tests::get_root_by_path_returns_none_when_not_found ... ok
[INFO] [stdout] test db::tests::enforce_ignored_directory_inheritance_ignores_descendants ... ok
[INFO] [stdout] test db::tests::get_stats_returns_defaults ... ok
[INFO] [stdout] test db::tests::insert_root_creates_new ... ok
[INFO] [stdout] test db::tests::insert_root_is_idempotent ... ok
[INFO] [stdout] test db::tests::list_entries_by_parent_excludes_removed ... ok
[INFO] [stdout] test db::tests::list_entries_by_parent_is_root_scoped_for_overlapping_paths ... ok
[INFO] [stdout] test db::tests::update_entry_status_fails_on_nonexistent ... ok
[INFO] [stdout] test db::tests::list_entries_by_parent_returns_children ... ok
[INFO] [stdout] test db::tests::stats_enforces_singleton_constraint ... ok
[INFO] [stdout] test db::tests::list_roots_returns_all_ordered_by_path ... ok
[INFO] [stdout] test db::tests::list_entries_by_root_excludes_removed ... ok
[INFO] [stdout] test removal::tests::check_removability_fails_for_nonexistent_path ... ok
[INFO] [stdout] test db::tests::update_root_last_scanned_works ... ok
[INFO] [stdout] test removal::tests::check_removability_succeeds_for_existing_directory ... ok
[INFO] [stdout] test db::tests::list_entries_by_root_and_status_filters_correctly ... ok
[INFO] [stdout] test removal::tests::check_removability_succeeds_for_existing_file ... ok
[INFO] [stdout] test db::tests::update_entry_status_rejects_invalid_status ... ok
[INFO] [stdout] test db::tests::list_entries_by_root_returns_all_descendants ... ok
[INFO] [stdout] test db::tests::update_entry_status_works ... ok
[INFO] [stdout] test db::tests::list_entries_filters_by_status ... ok
[INFO] [stdout] test db::tests::update_entries_by_path_prefix_updates_all_matching ... ok
[INFO] [stdout] test db::tests::upsert_entry_creates_new_directory ... ok
[INFO] [stdout] test db::tests::upsert_entry_allows_same_path_in_multiple_roots ... ok
[INFO] [stdout] test db::tests::upsert_entry_fails_with_invalid_root_id ... ok
[INFO] [stdout] test scanner::tests::calculate_expiration_handles_custom_expiration_period ... ok
[INFO] [stdout] test scanner::tests::calculate_expiration_returns_negative_for_expired_files ... ok
[INFO] [stdout] test scanner::tests::calculate_expiration_returns_positive_for_recent_files ... ok
[INFO] [stdout] test scanner::tests::calculate_expiration_returns_zero_on_expiration_day ... ok
[INFO] [stdout] test db::tests::upsert_entry_creates_new_file ... ok
[INFO] [stdout] test db::tests::upsert_entry_no_return_writes_entry ... ok
[INFO] [stdout] test removal::tests::dry_run_approved_ignores_non_approved_entries ... ok
[INFO] [stdout] test removal::tests::dry_run_approved_with_no_approved_entries ... ok
[INFO] [stdout] test db::tests::upsert_entry_updates_existing ... ok
[INFO] [stdout] test removal::tests::remove_approved_handles_nonexistent_path ... ok
[INFO] [stdout] test removal::tests::dry_run_approved_mixed_existing_and_nonexistent ... ok
[INFO] [stdout] test removal::tests::remove_approved_records_audit_entries_with_entry_id ... ok
[INFO] [stdout] test removal::tests::remove_approved_processes_approved_entries ... ok
[INFO] [stdout] test removal::tests::dry_run_approved_all_entries_exist ... ok
[INFO] [stdout] test removal::tests::remove_approved_handles_permission_denied ... FAILED
[INFO] [stdout] test removal::tests::remove_approved_returns_empty_summary_when_no_approved ... ok
[INFO] [stdout] test scanner::tests::cleanup_missing_entries_keeps_undiscovered_paths_if_they_still_exist ... ok
[INFO] [stdout] test removal::tests::remove_approved_handles_mixed_success_and_failure ... FAILED
[INFO] [stdout] test scanner::tests::cleanup_missing_entries_marks_nonexistent_paths_as_removed ... ok
[INFO] [stdout] test scanner::tests::expiration_uses_effective_timestamp ... ok
[INFO] [stdout] test scanner::tests::scan_and_persist_creates_root_and_entries ... ok
[INFO] [stdout] test scanner::tests::scan_and_persist_creates_file_entries ... ok
[INFO] [stdout] test scanner::tests::scanner_aggregates_by_directory ... ok
[INFO] [stdout] test scanner::tests::scanner_correctly_identifies_oldest_mtime ... ok
[INFO] [stdout] test scanner::tests::scan_and_persist_persists_empty_subdirectories ... ok
[INFO] [stdout] test scanner::tests::scanner_fails_on_nonexistent_path ... ok
[INFO] [stdout] test scanner::tests::scanner_fails_on_file_path ... ok
[INFO] [stdout] test scanner::tests::scanner_handles_empty_directory ... ok
[INFO] [stdout] test scanner::tests::scan_and_persist_new_files_in_ignored_directory_stay_ignored ... ok
[INFO] [stdout] test scanner::tests::scan_and_persist_sets_recursive_directory_sizes ... ok
[INFO] [stdout] test scanner::tests::scanner_includes_hidden_files ... ok
[INFO] [stdout] test scanner::tests::scanner_finds_all_files ... ok
[INFO] [stdout] test scanner::tests::scan_and_persist_records_audit_entry ... ok
[INFO] [stdout] test scanner::tests::scan_and_persist_handles_multiple_paths ... ok
[INFO] [stdout] test scanner::tests::scanner_skips_broken_symlinks_gracefully ... ok
[INFO] [stdout] test scanner::tests::scanner_resolves_symlinks ... ok
[INFO] [stdout] test scanner::tests::scan_and_persist_preserves_overlapping_entries_for_both_roots ... ok
[INFO] [stdout] test scanner::tests::scan_and_persist_updates_stats_table ... ok
[INFO] [stdout] test scanner::tests::scanner_tracks_oldest_mtime ... ok
[INFO] [stdout] test scanner::tests::scanner_includes_empty_directories ... ok
[INFO] [stdout] test scanner::tests::scan_and_persist_marks_removed_overlap_entries_per_root ... ok
[INFO] [stdout] test scanner::tests::scan_and_persist_ignored_inheritance_stays_root_local_for_overlap ... ok
[INFO] [stdout] test scanner::tests::scan_and_persist_upserts_existing_entries ... ok
[INFO] [stdout] test scanner::tests::scan_and_persist_updates_global_stats_with_deduped_overlap_totals ... ok
[INFO] [stdout] test scanner::tests::scan_sets_tracked_since_on_first_insert ... ok
[INFO] [stdout] test scanner::tests::transition_expired_paths_does_not_transition_non_expired ... ok
[INFO] [stdout] test scanner::tests::transition_expired_paths_does_not_reset_active_deferral ... ok
[INFO] [stdout] test scanner::tests::stats_update_handles_entries_without_mtime ... ok
[INFO] [stdout] test scanner::tests::stats_update_sets_last_scan_completed_timestamp ... ok
[INFO] [stdout] test scanner::tests::stats_update_calculates_files_pending_approval ... ok
[INFO] [stdout] test scanner::tests::transition_expired_paths_handles_deferred_with_null_deferred_until ... ok
[INFO] [stdout] test scanner::tests::transition_expired_paths_handles_empty_database ... ok
[INFO] [stdout] test scanner::tests::stats_update_calculates_files_within_warning ... ok
[INFO] [stdout] test scanner::tests::transition_expired_paths_handles_entry_without_mtime ... ok
[INFO] [stdout] test scanner::tests::stats_update_excludes_ignored_from_overdue_count ... ok
[INFO] [stdout] test scanner::tests::stats_update_custom_expiration_warning_periods ... ok
[INFO] [stdout] test scanner::tests::stats_update_calculates_files_overdue ... ok
[INFO] [stdout] test scanner::tests::stats_update_handles_mixed_scenarios ... ok
[INFO] [stdout] test scanner::tests::transition_expired_paths_ignores_ignored_status ... ok
[INFO] [stdout] test scanner::tests::transition_expired_paths_ignores_directories ... ok
[INFO] [stdout] test scanner::tests::transition_expired_paths_resets_expired_deferral ... ok
[INFO] [stdout] test scanner::tests::transition_expired_paths_moves_expired_tracked_to_pending ... ok
[INFO] [stdout] test scanner::tests::transition_expired_paths_moves_expired_tracked_to_approved_with_auto_remove ... ok
[INFO] [stdout] test scanner::tests::transition_expired_paths_ignores_pending_approved_removed_blocked ... ok
[INFO] [stdout] test scanner::tests::transition_expired_paths_handles_multiple_entries ... ok
[INFO] [stdout] test db::tests::upsert_entry_preserves_tracked_since ... ok
[INFO] [stdout] test db::tests::upsert_entry_revives_removed_path_as_tracked ... ok
[INFO] [stdout] test scanner::tests::scan_preserves_tracked_since_on_update ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- config::tests::local_config_unreadable_file_returns_error stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'config::tests::local_config_unreadable_file_returns_error' (77) panicked at src/config/mod.rs:949:9:
[INFO] [stdout] should fail on unreadable file
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5f300093c98a - std[fce30c26ee6459b]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5f300093c98a - std[fce30c26ee6459b]::backtrace_rs::backtrace::trace_unsynchronized::<std[fce30c26ee6459b]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5f300093c98a - std[fce30c26ee6459b]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5f300093c98a - <<std[fce30c26ee6459b]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[d17f6591d688f3bd]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5f30009542ba - <core[d17f6591d688f3bd]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5f30009542ba - core[d17f6591d688f3bd]::fmt::write
[INFO] [stdout]    6:     0x5f30009417c2 - std[fce30c26ee6459b]::io::default_write_fmt::<alloc[dad09f3a48280dba]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/io/mod.rs:621:11
[INFO] [stdout]    7:     0x5f30009417c2 - <alloc[dad09f3a48280dba]::vec::Vec<u8> as std[fce30c26ee6459b]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/io/mod.rs:1976:13
[INFO] [stdout]    8:     0x5f300091723f - <std[fce30c26ee6459b]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5f300091723f - std[fce30c26ee6459b]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5f3000932499 - std[fce30c26ee6459b]::panicking::default_hook
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5f30005353bc - <alloc[dad09f3a48280dba]::boxed::Box<dyn for<'a, 'b> core[d17f6591d688f3bd]::ops::function::Fn<(&'a std[fce30c26ee6459b]::panic::PanicHookInfo<'b>,), Output = ()> + core[d17f6591d688f3bd]::marker::Sync + core[d17f6591d688f3bd]::marker::Send> as core[d17f6591d688f3bd]::ops::function::Fn<(&std[fce30c26ee6459b]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   12:     0x5f30005353bc - test[9653f4f1d2ca1489]::test_main_inner::<test[9653f4f1d2ca1489]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5f3000932712 - <alloc[dad09f3a48280dba]::boxed::Box<dyn for<'a, 'b> core[d17f6591d688f3bd]::ops::function::Fn<(&'a std[fce30c26ee6459b]::panic::PanicHookInfo<'b>,), Output = ()> + core[d17f6591d688f3bd]::marker::Sync + core[d17f6591d688f3bd]::marker::Send> as core[d17f6591d688f3bd]::ops::function::Fn<(&std[fce30c26ee6459b]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   14:     0x5f3000932712 - std[fce30c26ee6459b]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5f300091732a - std[fce30c26ee6459b]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:691:13
[INFO] [stdout]   16:     0x5f300090c089 - std[fce30c26ee6459b]::sys::backtrace::__rust_end_short_backtrace::<std[fce30c26ee6459b]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5f30009183dd - __rustc[de152adb51f02556]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5f3000954b2c - core[d17f6591d688f3bd]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5f3000277885 - stagecrew[ce69dfb123acfc32]::config::tests::local_config_unreadable_file_returns_error
[INFO] [stdout]                                at /opt/rustwide/workdir/src/config/mod.rs:949:9
[INFO] [stdout]   20:     0x5f300026ee87 - stagecrew[ce69dfb123acfc32]::config::tests::local_config_unreadable_file_returns_error::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/config/mod.rs:934:52
[INFO] [stdout]   21:     0x5f3000361766 - <stagecrew[ce69dfb123acfc32]::config::tests::local_config_unreadable_file_returns_error::{closure#0} as core[d17f6591d688f3bd]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   22:     0x5f300052869b - <fn() -> core[d17f6591d688f3bd]::result::Result<(), alloc[dad09f3a48280dba]::string::String> as core[d17f6591d688f3bd]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x5f300052869b - test[9653f4f1d2ca1489]::__rust_begin_short_backtrace::<core[d17f6591d688f3bd]::result::Result<(), alloc[dad09f3a48280dba]::string::String>, fn() -> core[d17f6591d688f3bd]::result::Result<(), alloc[dad09f3a48280dba]::string::String>>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/test/src/lib.rs:724:18
[INFO] [stdout]   24:     0x5f3000535e8b - test[9653f4f1d2ca1489]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/test/src/lib.rs:747:74
[INFO] [stdout]   25:     0x5f3000535e8b - <core[d17f6591d688f3bd]::panic::unwind_safe::AssertUnwindSafe<test[9653f4f1d2ca1489]::run_test_in_process::{closure#0}> as core[d17f6591d688f3bd]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   26:     0x5f3000535e8b - std[fce30c26ee6459b]::panicking::catch_unwind::do_call::<core[d17f6591d688f3bd]::panic::unwind_safe::AssertUnwindSafe<test[9653f4f1d2ca1489]::run_test_in_process::{closure#0}>, core[d17f6591d688f3bd]::result::Result<(), alloc[dad09f3a48280dba]::string::String>>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:581:40
[INFO] [stdout]   27:     0x5f3000535e8b - std[fce30c26ee6459b]::panicking::catch_unwind::<core[d17f6591d688f3bd]::result::Result<(), alloc[dad09f3a48280dba]::string::String>, core[d17f6591d688f3bd]::panic::unwind_safe::AssertUnwindSafe<test[9653f4f1d2ca1489]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:544:19
[INFO] [stdout]   28:     0x5f3000535e8b - std[fce30c26ee6459b]::panic::catch_unwind::<core[d17f6591d688f3bd]::panic::unwind_safe::AssertUnwindSafe<test[9653f4f1d2ca1489]::run_test_in_process::{closure#0}>, core[d17f6591d688f3bd]::result::Result<(), alloc[dad09f3a48280dba]::string::String>>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panic.rs:359:14
[INFO] [stdout]   29:     0x5f3000535e8b - test[9653f4f1d2ca1489]::run_test_in_process
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/test/src/lib.rs:747:27
[INFO] [stdout]   30:     0x5f3000535e8b - test[9653f4f1d2ca1489]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/test/src/lib.rs:668:43
[INFO] [stdout]   31:     0x5f300052f5a4 - test[9653f4f1d2ca1489]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/test/src/lib.rs:698:41
[INFO] [stdout]   32:     0x5f300052f5a4 - std[fce30c26ee6459b]::sys::backtrace::__rust_begin_short_backtrace::<test[9653f4f1d2ca1489]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   33:     0x5f3000538a92 - std[fce30c26ee6459b]::thread::lifecycle::spawn_unchecked::<test[9653f4f1d2ca1489]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   34:     0x5f3000538a92 - <core[d17f6591d688f3bd]::panic::unwind_safe::AssertUnwindSafe<std[fce30c26ee6459b]::thread::lifecycle::spawn_unchecked<test[9653f4f1d2ca1489]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[d17f6591d688f3bd]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   35:     0x5f3000538a92 - std[fce30c26ee6459b]::panicking::catch_unwind::do_call::<core[d17f6591d688f3bd]::panic::unwind_safe::AssertUnwindSafe<std[fce30c26ee6459b]::thread::lifecycle::spawn_unchecked<test[9653f4f1d2ca1489]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:581:40
[INFO] [stdout]   36:     0x5f3000538a92 - std[fce30c26ee6459b]::panicking::catch_unwind::<(), core[d17f6591d688f3bd]::panic::unwind_safe::AssertUnwindSafe<std[fce30c26ee6459b]::thread::lifecycle::spawn_unchecked<test[9653f4f1d2ca1489]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:544:19
[INFO] [stdout]   37:     0x5f3000538a92 - std[fce30c26ee6459b]::panic::catch_unwind::<core[d17f6591d688f3bd]::panic::unwind_safe::AssertUnwindSafe<std[fce30c26ee6459b]::thread::lifecycle::spawn_unchecked<test[9653f4f1d2ca1489]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panic.rs:359:14
[INFO] [stdout]   38:     0x5f3000538a92 - std[fce30c26ee6459b]::thread::lifecycle::spawn_unchecked::<test[9653f4f1d2ca1489]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   39:     0x5f3000538a92 - <std[fce30c26ee6459b]::thread::lifecycle::spawn_unchecked<test[9653f4f1d2ca1489]::run_test::{closure#1}, ()>::{closure#1} as core[d17f6591d688f3bd]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   40:     0x5f300093b98f - <alloc[dad09f3a48280dba]::boxed::Box<dyn core[d17f6591d688f3bd]::ops::function::FnOnce<(), Output = ()> + core[d17f6591d688f3bd]::marker::Send> as core[d17f6591d688f3bd]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/alloc/src/boxed.rs:2271:9
[INFO] [stdout]   41:     0x5f300093b98f - <std[fce30c26ee6459b]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   42:     0x7100c1328aa4 - <unknown>
[INFO] [stdout]   43:     0x7100c13b5a64 - clone
[INFO] [stdout]   44:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- removal::tests::remove_approved_handles_permission_denied stdout ----
[INFO] [stdout] 2026-05-05T23:01:43.150584Z  INFO stagecrew::db: Migrating entries table to root-scoped uniqueness
[INFO] [stdout] 2026-05-05T23:01:43.172155Z  INFO stagecrew::db: entries table migration complete
[INFO] [stdout] 2026-05-05T23:01:43.207333Z DEBUG stagecrew::removal: Processing approved entry for removal path="/tmp/stagecrew-removal-files-ctHy2x/protected" is_dir=true
[INFO] [stdout] 2026-05-05T23:01:43.207573Z  INFO stagecrew::removal: Permanently deleted path="/tmp/stagecrew-removal-files-ctHy2x/protected"
[INFO] [stdout] 2026-05-05T23:01:43.225892Z  INFO stagecrew::removal: Entry removed successfully path="/tmp/stagecrew-removal-files-ctHy2x/protected" bytes=28
[INFO] [stdout] 2026-05-05T23:01:43.228919Z  INFO stagecrew::audit: audit_event audit_action="remove" audit_user="unknown" audit_actor_source="daemon" audit_target_path="/tmp/stagecrew-removal-files-ctHy2x/protected" audit_entry_id=1 audit_root_id=1 audit_status_before="approved" audit_status_after="removed" audit_outcome="removed" audit_details="Permanently deleted 28 bytes"
[INFO] [stdout] 
[INFO] [stdout] thread 'removal::tests::remove_approved_handles_permission_denied' (136) panicked at src/removal/mod.rs:523:9:
[INFO] [stdout] assertion `left == right` failed: Expected no entries removed
[INFO] [stdout]   left: 1
[INFO] [stdout]  right: 0
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5f300093c98a - std[fce30c26ee6459b]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5f300093c98a - std[fce30c26ee6459b]::backtrace_rs::backtrace::trace_unsynchronized::<std[fce30c26ee6459b]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5f300093c98a - std[fce30c26ee6459b]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5f300093c98a - <<std[fce30c26ee6459b]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[d17f6591d688f3bd]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5f30009542ba - <core[d17f6591d688f3bd]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5f30009542ba - core[d17f6591d688f3bd]::fmt::write
[INFO] [stdout]    6:     0x5f30009417c2 - std[fce30c26ee6459b]::io::default_write_fmt::<alloc[dad09f3a48280dba]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/io/mod.rs:621:11
[INFO] [stdout]    7:     0x5f30009417c2 - <alloc[dad09f3a48280dba]::vec::Vec<u8> as std[fce30c26ee6459b]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/io/mod.rs:1976:13
[INFO] [stdout]    8:     0x5f300091723f - <std[fce30c26ee6459b]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5f300091723f - std[fce30c26ee6459b]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5f3000932499 - std[fce30c26ee6459b]::panicking::default_hook
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5f30005353bc - <alloc[dad09f3a48280dba]::boxed::Box<dyn for<'a, 'b> core[d17f6591d688f3bd]::ops::function::Fn<(&'a std[fce30c26ee6459b]::panic::PanicHookInfo<'b>,), Output = ()> + core[d17f6591d688f3bd]::marker::Sync + core[d17f6591d688f3bd]::marker::Send> as core[d17f6591d688f3bd]::ops::function::Fn<(&std[fce30c26ee6459b]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   12:     0x5f30005353bc - test[9653f4f1d2ca1489]::test_main_inner::<test[9653f4f1d2ca1489]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5f3000932712 - <alloc[dad09f3a48280dba]::boxed::Box<dyn for<'a, 'b> core[d17f6591d688f3bd]::ops::function::Fn<(&'a std[fce30c26ee6459b]::panic::PanicHookInfo<'b>,), Output = ()> + core[d17f6591d688f3bd]::marker::Sync + core[d17f6591d688f3bd]::marker::Send> as core[d17f6591d688f3bd]::ops::function::Fn<(&std[fce30c26ee6459b]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   14:     0x5f3000932712 - std[fce30c26ee6459b]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5f30009172f8 - std[fce30c26ee6459b]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5f300090c089 - std[fce30c26ee6459b]::sys::backtrace::__rust_end_short_backtrace::<std[fce30c26ee6459b]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5f30009183dd - __rustc[de152adb51f02556]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5f3000954b2c - core[d17f6591d688f3bd]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5f3000954a13 - core[d17f6591d688f3bd]::panicking::assert_failed_inner
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/core/src/panicking.rs:434:23
[INFO] [stdout]   20:     0x5f300094f38d - core[d17f6591d688f3bd]::panicking::assert_failed::<usize, usize>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/core/src/panicking.rs:394:5
[INFO] [stdout]   21:     0x5f30002f0e02 - stagecrew[ce69dfb123acfc32]::removal::tests::remove_approved_handles_permission_denied
[INFO] [stdout]                                at /opt/rustwide/workdir/src/removal/mod.rs:523:9
[INFO] [stdout]   22:     0x5f30002ebb07 - stagecrew[ce69dfb123acfc32]::removal::tests::remove_approved_handles_permission_denied::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/removal/mod.rs:483:51
[INFO] [stdout]   23:     0x5f3000361ae6 - <stagecrew[ce69dfb123acfc32]::removal::tests::remove_approved_handles_permission_denied::{closure#0} as core[d17f6591d688f3bd]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x5f300052869b - <fn() -> core[d17f6591d688f3bd]::result::Result<(), alloc[dad09f3a48280dba]::string::String> as core[d17f6591d688f3bd]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5f300052869b - test[9653f4f1d2ca1489]::__rust_begin_short_backtrace::<core[d17f6591d688f3bd]::result::Result<(), alloc[dad09f3a48280dba]::string::String>, fn() -> core[d17f6591d688f3bd]::result::Result<(), alloc[dad09f3a48280dba]::string::String>>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/test/src/lib.rs:724:18
[INFO] [stdout]   26:     0x5f3000535e8b - test[9653f4f1d2ca1489]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/test/src/lib.rs:747:74
[INFO] [stdout]   27:     0x5f3000535e8b - <core[d17f6591d688f3bd]::panic::unwind_safe::AssertUnwindSafe<test[9653f4f1d2ca1489]::run_test_in_process::{closure#0}> as core[d17f6591d688f3bd]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   28:     0x5f3000535e8b - std[fce30c26ee6459b]::panicking::catch_unwind::do_call::<core[d17f6591d688f3bd]::panic::unwind_safe::AssertUnwindSafe<test[9653f4f1d2ca1489]::run_test_in_process::{closure#0}>, core[d17f6591d688f3bd]::result::Result<(), alloc[dad09f3a48280dba]::string::String>>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:581:40
[INFO] [stdout]   29:     0x5f3000535e8b - std[fce30c26ee6459b]::panicking::catch_unwind::<core[d17f6591d688f3bd]::result::Result<(), alloc[dad09f3a48280dba]::string::String>, core[d17f6591d688f3bd]::panic::unwind_safe::AssertUnwindSafe<test[9653f4f1d2ca1489]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:544:19
[INFO] [stdout]   30:     0x5f3000535e8b - std[fce30c26ee6459b]::panic::catch_unwind::<core[d17f6591d688f3bd]::panic::unwind_safe::AssertUnwindSafe<test[9653f4f1d2ca1489]::run_test_in_process::{closure#0}>, core[d17f6591d688f3bd]::result::Result<(), alloc[dad09f3a48280dba]::string::String>>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x5f3000535e8b - test[9653f4f1d2ca1489]::run_test_in_process
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/test/src/lib.rs:747:27
[INFO] [stdout]   32:     0x5f3000535e8b - test[9653f4f1d2ca1489]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/test/src/lib.rs:668:43
[INFO] [stdout]   33:     0x5f300052f5a4 - test[9653f4f1d2ca1489]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/test/src/lib.rs:698:41
[INFO] [stdout]   34:     0x5f300052f5a4 - std[fce30c26ee6459b]::sys::backtrace::__rust_begin_short_backtrace::<test[9653f4f1d2ca1489]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x5f3000538a92 - std[fce30c26ee6459b]::thread::lifecycle::spawn_unchecked::<test[9653f4f1d2ca1489]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   36:     0x5f3000538a92 - <core[d17f6591d688f3bd]::panic::unwind_safe::AssertUnwindSafe<std[fce30c26ee6459b]::thread::lifecycle::spawn_unchecked<test[9653f4f1d2ca1489]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[d17f6591d688f3bd]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   37:     0x5f3000538a92 - std[fce30c26ee6459b]::panicking::catch_unwind::do_call::<core[d17f6591d688f3bd]::panic::unwind_safe::AssertUnwindSafe<std[fce30c26ee6459b]::thread::lifecycle::spawn_unchecked<test[9653f4f1d2ca1489]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:581:40
[INFO] [stdout]   38:     0x5f3000538a92 - std[fce30c26ee6459b]::panicking::catch_unwind::<(), core[d17f6591d688f3bd]::panic::unwind_safe::AssertUnwindSafe<std[fce30c26ee6459b]::thread::lifecycle::spawn_unchecked<test[9653f4f1d2ca1489]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:544:19
[INFO] [stdout]   39:     0x5f3000538a92 - std[fce30c26ee6459b]::panic::catch_unwind::<core[d17f6591d688f3bd]::panic::unwind_safe::AssertUnwindSafe<std[fce30c26ee6459b]::thread::lifecycle::spawn_unchecked<test[9653f4f1d2ca1489]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x5f3000538a92 - std[fce30c26ee6459b]::thread::lifecycle::spawn_unchecked::<test[9653f4f1d2ca1489]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   41:     0x5f3000538a92 - <std[fce30c26ee6459b]::thread::lifecycle::spawn_unchecked<test[9653f4f1d2ca1489]::run_test::{closure#1}, ()>::{closure#1} as core[d17f6591d688f3bd]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x5f300093b98f - <alloc[dad09f3a48280dba]::boxed::Box<dyn core[d17f6591d688f3bd]::ops::function::FnOnce<(), Output = ()> + core[d17f6591d688f3bd]::marker::Send> as core[d17f6591d688f3bd]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/alloc/src/boxed.rs:2271:9
[INFO] [stdout]   43:     0x5f300093b98f - <std[fce30c26ee6459b]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   44:     0x7100c1328aa4 - <unknown>
[INFO] [stdout]   45:     0x7100c13b5a64 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- removal::tests::remove_approved_handles_mixed_success_and_failure stdout ----
[INFO] [stdout] 2026-05-05T23:01:43.152847Z  INFO stagecrew::db: Migrating entries table to root-scoped uniqueness
[INFO] [stdout] 2026-05-05T23:01:43.180014Z  INFO stagecrew::db: entries table migration complete
[INFO] [stdout] 2026-05-05T23:01:43.232684Z DEBUG stagecrew::removal: Processing approved entry for removal path="/tmp/stagecrew-removal-files-OZpHXt/normal" is_dir=true
[INFO] [stdout] 2026-05-05T23:01:43.234865Z  INFO stagecrew::removal: Permanently deleted path="/tmp/stagecrew-removal-files-OZpHXt/normal"
[INFO] [stdout] 2026-05-05T23:01:43.241329Z  INFO stagecrew::removal: Entry removed successfully path="/tmp/stagecrew-removal-files-OZpHXt/normal" bytes=28
[INFO] [stdout] 2026-05-05T23:01:43.244189Z  INFO stagecrew::audit: audit_event audit_action="remove" audit_user="unknown" audit_actor_source="daemon" audit_target_path="/tmp/stagecrew-removal-files-OZpHXt/normal" audit_entry_id=1 audit_root_id=1 audit_status_before="approved" audit_status_after="removed" audit_outcome="removed" audit_details="Permanently deleted 28 bytes"
[INFO] [stdout] 2026-05-05T23:01:43.244235Z DEBUG stagecrew::removal: Processing approved entry for removal path="/tmp/stagecrew-removal-files-OZpHXt/protected" is_dir=true
[INFO] [stdout] 2026-05-05T23:01:43.245060Z  INFO stagecrew::removal: Permanently deleted path="/tmp/stagecrew-removal-files-OZpHXt/protected"
[INFO] [stdout] 2026-05-05T23:01:43.248261Z  INFO stagecrew::removal: Entry removed successfully path="/tmp/stagecrew-removal-files-OZpHXt/protected" bytes=28
[INFO] [stdout] 2026-05-05T23:01:43.251196Z  INFO stagecrew::audit: audit_event audit_action="remove" audit_user="unknown" audit_actor_source="daemon" audit_target_path="/tmp/stagecrew-removal-files-OZpHXt/protected" audit_entry_id=2 audit_root_id=1 audit_status_before="approved" audit_status_after="removed" audit_outcome="removed" audit_details="Permanently deleted 28 bytes"
[INFO] [stdout] 
[INFO] [stdout] thread 'removal::tests::remove_approved_handles_mixed_success_and_failure' (134) panicked at src/removal/mod.rs:664:9:
[INFO] [stdout] assertion `left == right` failed: Expected 1 entry removed
[INFO] [stdout]   left: 2
[INFO] [stdout]  right: 1
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5f300093c98a - std[fce30c26ee6459b]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5f300093c98a - std[fce30c26ee6459b]::backtrace_rs::backtrace::trace_unsynchronized::<std[fce30c26ee6459b]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5f300093c98a - std[fce30c26ee6459b]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5f300093c98a - <<std[fce30c26ee6459b]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[d17f6591d688f3bd]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5f30009542ba - <core[d17f6591d688f3bd]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5f30009542ba - core[d17f6591d688f3bd]::fmt::write
[INFO] [stdout]    6:     0x5f30009417c2 - std[fce30c26ee6459b]::io::default_write_fmt::<alloc[dad09f3a48280dba]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/io/mod.rs:621:11
[INFO] [stdout]    7:     0x5f30009417c2 - <alloc[dad09f3a48280dba]::vec::Vec<u8> as std[fce30c26ee6459b]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/io/mod.rs:1976:13
[INFO] [stdout]    8:     0x5f300091723f - <std[fce30c26ee6459b]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5f300091723f - std[fce30c26ee6459b]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5f3000932499 - std[fce30c26ee6459b]::panicking::default_hook
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5f30005353bc - <alloc[dad09f3a48280dba]::boxed::Box<dyn for<'a, 'b> core[d17f6591d688f3bd]::ops::function::Fn<(&'a std[fce30c26ee6459b]::panic::PanicHookInfo<'b>,), Output = ()> + core[d17f6591d688f3bd]::marker::Sync + core[d17f6591d688f3bd]::marker::Send> as core[d17f6591d688f3bd]::ops::function::Fn<(&std[fce30c26ee6459b]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   12:     0x5f30005353bc - test[9653f4f1d2ca1489]::test_main_inner::<test[9653f4f1d2ca1489]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5f3000932712 - <alloc[dad09f3a48280dba]::boxed::Box<dyn for<'a, 'b> core[d17f6591d688f3bd]::ops::function::Fn<(&'a std[fce30c26ee6459b]::panic::PanicHookInfo<'b>,), Output = ()> + core[d17f6591d688f3bd]::marker::Sync + core[d17f6591d688f3bd]::marker::Send> as core[d17f6591d688f3bd]::ops::function::Fn<(&std[fce30c26ee6459b]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   14:     0x5f3000932712 - std[fce30c26ee6459b]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5f30009172f8 - std[fce30c26ee6459b]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5f300090c089 - std[fce30c26ee6459b]::sys::backtrace::__rust_end_short_backtrace::<std[fce30c26ee6459b]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5f30009183dd - __rustc[de152adb51f02556]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5f3000954b2c - core[d17f6591d688f3bd]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5f3000954a13 - core[d17f6591d688f3bd]::panicking::assert_failed_inner
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/core/src/panicking.rs:434:23
[INFO] [stdout]   20:     0x5f300094f38d - core[d17f6591d688f3bd]::panicking::assert_failed::<usize, usize>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/core/src/panicking.rs:394:5
[INFO] [stdout]   21:     0x5f30002f4001 - stagecrew[ce69dfb123acfc32]::removal::tests::remove_approved_handles_mixed_success_and_failure
[INFO] [stdout]                                at /opt/rustwide/workdir/src/removal/mod.rs:664:9
[INFO] [stdout]   22:     0x5f30002ebc27 - stagecrew[ce69dfb123acfc32]::removal::tests::remove_approved_handles_mixed_success_and_failure::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/removal/mod.rs:611:59
[INFO] [stdout]   23:     0x5f3000361c66 - <stagecrew[ce69dfb123acfc32]::removal::tests::remove_approved_handles_mixed_success_and_failure::{closure#0} as core[d17f6591d688f3bd]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x5f300052869b - <fn() -> core[d17f6591d688f3bd]::result::Result<(), alloc[dad09f3a48280dba]::string::String> as core[d17f6591d688f3bd]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5f300052869b - test[9653f4f1d2ca1489]::__rust_begin_short_backtrace::<core[d17f6591d688f3bd]::result::Result<(), alloc[dad09f3a48280dba]::string::String>, fn() -> core[d17f6591d688f3bd]::result::Result<(), alloc[dad09f3a48280dba]::string::String>>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/test/src/lib.rs:724:18
[INFO] [stdout]   26:     0x5f3000535e8b - test[9653f4f1d2ca1489]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/test/src/lib.rs:747:74
[INFO] [stdout]   27:     0x5f3000535e8b - <core[d17f6591d688f3bd]::panic::unwind_safe::AssertUnwindSafe<test[9653f4f1d2ca1489]::run_test_in_process::{closure#0}> as core[d17f6591d688f3bd]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   28:     0x5f3000535e8b - std[fce30c26ee6459b]::panicking::catch_unwind::do_call::<core[d17f6591d688f3bd]::panic::unwind_safe::AssertUnwindSafe<test[9653f4f1d2ca1489]::run_test_in_process::{closure#0}>, core[d17f6591d688f3bd]::result::Result<(), alloc[dad09f3a48280dba]::string::String>>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:581:40
[INFO] [stdout]   29:     0x5f3000535e8b - std[fce30c26ee6459b]::panicking::catch_unwind::<core[d17f6591d688f3bd]::result::Result<(), alloc[dad09f3a48280dba]::string::String>, core[d17f6591d688f3bd]::panic::unwind_safe::AssertUnwindSafe<test[9653f4f1d2ca1489]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:544:19
[INFO] [stdout]   30:     0x5f3000535e8b - std[fce30c26ee6459b]::panic::catch_unwind::<core[d17f6591d688f3bd]::panic::unwind_safe::AssertUnwindSafe<test[9653f4f1d2ca1489]::run_test_in_process::{closure#0}>, core[d17f6591d688f3bd]::result::Result<(), alloc[dad09f3a48280dba]::string::String>>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x5f3000535e8b - test[9653f4f1d2ca1489]::run_test_in_process
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/test/src/lib.rs:747:27
[INFO] [stdout]   32:     0x5f3000535e8b - test[9653f4f1d2ca1489]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/test/src/lib.rs:668:43
[INFO] [stdout]   33:     0x5f300052f5a4 - test[9653f4f1d2ca1489]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/test/src/lib.rs:698:41
[INFO] [stdout]   34:     0x5f300052f5a4 - std[fce30c26ee6459b]::sys::backtrace::__rust_begin_short_backtrace::<test[9653f4f1d2ca1489]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x5f3000538a92 - std[fce30c26ee6459b]::thread::lifecycle::spawn_unchecked::<test[9653f4f1d2ca1489]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   36:     0x5f3000538a92 - <core[d17f6591d688f3bd]::panic::unwind_safe::AssertUnwindSafe<std[fce30c26ee6459b]::thread::lifecycle::spawn_unchecked<test[9653f4f1d2ca1489]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[d17f6591d688f3bd]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   37:     0x5f3000538a92 - std[fce30c26ee6459b]::panicking::catch_unwind::do_call::<core[d17f6591d688f3bd]::panic::unwind_safe::AssertUnwindSafe<std[fce30c26ee6459b]::thread::lifecycle::spawn_unchecked<test[9653f4f1d2ca1489]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:581:40
[INFO] [stdout]   38:     0x5f3000538a92 - std[fce30c26ee6459b]::panicking::catch_unwind::<(), core[d17f6591d688f3bd]::panic::unwind_safe::AssertUnwindSafe<std[fce30c26ee6459b]::thread::lifecycle::spawn_unchecked<test[9653f4f1d2ca1489]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panicking.rs:544:19
[INFO] [stdout]   39:     0x5f3000538a92 - std[fce30c26ee6459b]::panic::catch_unwind::<core[d17f6591d688f3bd]::panic::unwind_safe::AssertUnwindSafe<std[fce30c26ee6459b]::thread::lifecycle::spawn_unchecked<test[9653f4f1d2ca1489]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x5f3000538a92 - std[fce30c26ee6459b]::thread::lifecycle::spawn_unchecked::<test[9653f4f1d2ca1489]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   41:     0x5f3000538a92 - <std[fce30c26ee6459b]::thread::lifecycle::spawn_unchecked<test[9653f4f1d2ca1489]::run_test::{closure#1}, ()>::{closure#1} as core[d17f6591d688f3bd]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x5f300093b98f - <alloc[dad09f3a48280dba]::boxed::Box<dyn core[d17f6591d688f3bd]::ops::function::FnOnce<(), Output = ()> + core[d17f6591d688f3bd]::marker::Send> as core[d17f6591d688f3bd]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/alloc/src/boxed.rs:2271:9
[INFO] [stdout]   43:     0x5f300093b98f - <std[fce30c26ee6459b]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/b8e88e5ddf5521a9f43ee3f62a702388c713e4bb/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   44:     0x7100c1328aa4 - <unknown>
[INFO] [stdout]   45:     0x7100c13b5a64 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     config::tests::local_config_unreadable_file_returns_error
[INFO] [stdout]     removal::tests::remove_approved_handles_mixed_success_and_failure
[INFO] [stdout]     removal::tests::remove_approved_handles_permission_denied
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 172 passed; 3 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.14s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "cc1747b37750fe4f253007c41649bde91668f6eb078a13a174584af77706ecbe", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "cc1747b37750fe4f253007c41649bde91668f6eb078a13a174584af77706ecbe", kill_on_drop: false }`
[INFO] [stdout] cc1747b37750fe4f253007c41649bde91668f6eb078a13a174584af77706ecbe
